[INFO] fetching crate rubin 0.4.0...
[INFO] testing rubin-0.4.0 against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065-1
[INFO] extracting crate rubin 0.4.0 into /workspace/builds/worker-7-tc2/source
[INFO] started tweaking crates.io crate rubin 0.4.0
[INFO] finished tweaking crates.io crate rubin 0.4.0
[INFO] tweaked toml for crates.io crate rubin 0.4.0 written to /workspace/builds/worker-7-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate rubin 0.4.0 on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]      Locking 53 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] e68633798917eda6962e96f9a5b46e874cf40ce420d4c61f5066ed009849f099
[INFO] running `Command { std: "docker" "start" "-a" "e68633798917eda6962e96f9a5b46e874cf40ce420d4c61f5066ed009849f099", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "e68633798917eda6962e96f9a5b46e874cf40ce420d4c61f5066ed009849f099", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "e68633798917eda6962e96f9a5b46e874cf40ce420d4c61f5066ed009849f099", kill_on_drop: false }`
[INFO] [stdout] e68633798917eda6962e96f9a5b46e874cf40ce420d4c61f5066ed009849f099
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] d7dbd97823afda9e730825d39ac48e00ba282d6f73e6204fcd0dba19ee1db711
[INFO] running `Command { std: "docker" "start" "-a" "d7dbd97823afda9e730825d39ac48e00ba282d6f73e6204fcd0dba19ee1db711", kill_on_drop: false }`
[INFO] [stderr]    Compiling tracing-log v0.2.0
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling tracing v0.1.44
[INFO] [stderr]    Compiling serde_json v1.0.149
[INFO] [stderr]    Compiling tracing-subscriber v0.3.23
[INFO] [stderr]    Compiling rubin v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 3.41s
[INFO] running `Command { std: "docker" "inspect" "d7dbd97823afda9e730825d39ac48e00ba282d6f73e6204fcd0dba19ee1db711", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "d7dbd97823afda9e730825d39ac48e00ba282d6f73e6204fcd0dba19ee1db711", kill_on_drop: false }`
[INFO] [stdout] d7dbd97823afda9e730825d39ac48e00ba282d6f73e6204fcd0dba19ee1db711
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 382290476e91c3e88c675b8bac02faffbb8b5e2cf421889fb416f37d8de7cc91
[INFO] running `Command { std: "docker" "start" "-a" "382290476e91c3e88c675b8bac02faffbb8b5e2cf421889fb416f37d8de7cc91", kill_on_drop: false }`
[INFO] [stderr]    Compiling remove_dir_all v0.5.3
[INFO] [stderr]    Compiling tempdir v0.3.7
[INFO] [stderr]    Compiling rubin v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 2.62s
[INFO] running `Command { std: "docker" "inspect" "382290476e91c3e88c675b8bac02faffbb8b5e2cf421889fb416f37d8de7cc91", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "382290476e91c3e88c675b8bac02faffbb8b5e2cf421889fb416f37d8de7cc91", kill_on_drop: false }`
[INFO] [stdout] 382290476e91c3e88c675b8bac02faffbb8b5e2cf421889fb416f37d8de7cc91
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-7-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 1da2d61623ecbdc6b633ca65a26f640fa66b3800adc9710139940e74a4104ca4
[INFO] running `Command { std: "docker" "start" "-a" "1da2d61623ecbdc6b633ca65a26f640fa66b3800adc9710139940e74a4104ca4", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.07s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/rubin-309b22cfa2e9ca52)
[INFO] [stdout] 
[INFO] [stdout] running 41 tests
[INFO] [stdout] test net::parser::tests::create_appropriate_operation ... ok
[INFO] [stdout] test net::parser::tests::parse_invalid_requests ... ok
[INFO] [stdout] test net::parser::tests::create_appropriate_request ... ok
[INFO] [stdout] test net::parser::tests::parse_requests_correctly ... ok
[INFO] [stdout] test net::parser::tests::validate_decrement ... ok
[INFO] [stdout] test net::parser::tests::validate_increment ... ok
[INFO] [stdout] test net::parser::tests::validate_string_remove_message ... ok
[INFO] [stdout] test net::parser::tests::parses_an_invalid_response_correctly ... ok
[INFO] [stdout] test net::parser::tests::validation_dump_message ... ok
[INFO] [stdout] test net::parser::tests::validation_string_clear ... ok
[INFO] [stdout] test net::parser::tests::validation_string_get_message ... ok
[INFO] [stdout] test net::parser::tests::validation_string_set_message ... ok
[INFO] [stdout] test net::parser::tests::validation_noop_message ... ok
[INFO] [stdout] test store::mem::memstore::decrementer_multiple_keys ... ok
[INFO] [stdout] test store::mem::memstore::string_store_get_entries ... ok
[INFO] [stdout] test net::parser::tests::detects_an_invalid_message ... ok
[INFO] [stdout] test store::mem::memstore::string_store_no_entries ... ok
[INFO] [stdout] test store::mem::memstore::decrementer ... ok
[INFO] [stdout] test store::mem::memstore::clear_string_store ... ok
[INFO] [stdout] test store::mem::memstore::string_store_add_entries ... ok
[INFO] [stdout] test store::mem::memstore::empty ... ok
[INFO] [stdout] test store::mem::memstore::incrementer_multiple_keys ... ok
[INFO] [stdout] test store::mem::memstore::incrementer ... ok
[INFO] [stdout] test net::parser::tests::parses_a_valid_response ... ok
[INFO] [stdout] test store::mem::memstore::dump_store_to_disk ... ok
[INFO] [stdout] test store::persistence::file_handling::fh_tests::loading_an_empty_store ... ok
[INFO] [stdout] test store::persistence::file_handling::fh_tests::loading_an_existing_store ... ok
[INFO] [stdout] test store::persistence::file_handling::fh_tests::creating_a_directory ... ok
[INFO] [stdout] test store::persistence::persistent_store::load_from_memstore ... ok
[INFO] [stdout] test store::persistence::file_handling::fh_tests::write_a_store_out_and_compare ... FAILED
[INFO] [stdout] test store::persistence::persistent_store::empty_store ... ok
[INFO] [stdout] test store::persistence::persistent_store::add_and_write ... ok
[INFO] [stdout] test store::persistence::file_handling::fh_tests::write_a_store_out ... ok
[INFO] [stdout] test store::persistence::persistent_store::write_out_store ... ok
[INFO] [stdout] test store::persistence::file_handling::fh_tests::write_a_store_out_sync ... ok
[INFO] [stdout] test store::persistence::persistent_store::setting_write_on_update ... ok
[INFO] [stdout] test store::persistence::persistent_store::load_existing_store ... ok
[INFO] [stdout] test store::mem::memstore::string_store_add_loads_of_entries ... ok
[INFO] [stderr] error: test failed, to rerun pass `--lib`
[INFO] [stdout] test store::persistence::persistent_store::add_a_load_of_strings ... ok
[INFO] [stdout] test store::persistence::persistent_store::add_string_and_decrement_counter ... ok
[INFO] [stdout] test store::persistence::persistent_store::add_string_and_increment_counter ... ok
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout] 
[INFO] [stdout] ---- store::persistence::file_handling::fh_tests::write_a_store_out_and_compare stdout ----
[INFO] [stdout] Error: Custom { kind: UnexpectedEof, error: Error("EOF while parsing a value", line: 1, column: 0) }
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] failures:
[INFO] [stdout]     store::persistence::file_handling::fh_tests::write_a_store_out_and_compare
[INFO] [stdout] 
[INFO] [stdout] test result: FAILED. 40 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.50s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "1da2d61623ecbdc6b633ca65a26f640fa66b3800adc9710139940e74a4104ca4", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "1da2d61623ecbdc6b633ca65a26f640fa66b3800adc9710139940e74a4104ca4", kill_on_drop: false }`
[INFO] [stdout] 1da2d61623ecbdc6b633ca65a26f640fa66b3800adc9710139940e74a4104ca4
